[2017.09.19 15:42:57] [0000m.00s.048ms] [1] FlowInstallVersion: WARNING: Could not get flow install version file [InstallVersion.txt] creation time
[2017.09.19 15:42:57] [0000m.00s.055ms] [0] WELCOME
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] iCDB Server ver.1.094, vt40T8RtWJOG2cE2Nlvc5A, build:535943 created 2013-01-08 09:09:26, sources stamp:vt40T8RtWJOG2cE2Nlvc5A
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Copyright 2013 Mentor Graphics Corporation. All Rights Reserved.
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Base flow version [7.9.4]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] GBS Install Id [26418], Flow Id [EE7.9.4], Full Flow Name [Expedition Enterprise Flow], Exact Access Date [Jun 1 2012]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] UPDATE Install Info, GBS Install Id [29736], UPDATE Name [Expedition Enterprise Flow - Update 10 for EE7.9.4]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Machine [W2130]  User [levk]  PID [8180]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Operating system [Microsoft Windows 7 Business Edition, 64-bit Service Pack 1 (build 7601)]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Current working dir [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] PATH [C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\xe\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\wg\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\bin;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.4EE\MGC_HOME.ixn\bin;C:\MentorGraphics\7.9.4EE\MGC_HOME.ixn\lib;C:\Program Files\Common Files\Microsoft Shared\Microsoft Online Services;C:\Program Files (x86)\Common Files\Microsoft Shared\Microsoft Online Services;C:\ProgramData\Oracle\Java\javapath;C:\MentorGraphics\Allegro Export ODB++\nv\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\Common Files\Acronis\SnapAPI\;C:\Program Files (x86)\Altium Designer S09 Viewer\System;C:\Program Files\Aladdin\eToken\PKIClient\x32;C:\Program Files\Aladdin\eToken\PKIClient\x64;C:\Program Files\TortoiseSVN\bin;C:\Program Files (x86)\Skype\Phone\;C:\Cadence\SPB_16.6\openaccess\bin\win32\opt;C:\Cadence\SPB_16.6\tools\capture;C:\Cadence\SPB_16.6\tools\pspice;C:\Cadence\SPB_16.6\tools\specctra\bin;C:\Cadence\SPB_16.6\tools\fet\bin;C:\Cadence\SPB_16.6\tools\libutil\bin;C:\Cadence\SPB_16.6\tools\bin;C:\Cadence\SPB_16.6\tools\pcb\bin;;C:\MentorGraphics\7.9.4EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\7.9.5EE\SDD_HOME\common\win32\lib;C:\MentorGraphics\1.0CCASM\SDD_HOME\common\win32\lib]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] SDD_HOME [C:\MentorGraphics\7.9.4EE\SDD_HOME] on file system [NTFS]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] SDD_PLATFORM [win32]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] WDIR [C:\WDIR\7.9.4EE;C:\MentorGraphics\7.9.4EE\SDD_HOME\standard]
[2017.09.19 15:42:57] [0000m.00s.055ms] [1] Local iCDB working dir [C:\WDIR\7.9.4EE\iCDB] on file system [NTFS]
[2017.09.19 15:42:57] [0000m.00s.058ms] [1] S: Config file name [ServerWG.cfg]
[2017.09.19 15:42:57] [0000m.00s.058ms] [2] S: Loading config files
[2017.09.19 15:42:57] [0000m.00s.070ms] [1] Config file [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\cdbsvr\ServerWG.cfg] not found
[2017.09.19 15:42:57] [0000m.00s.070ms] [1] Config: Non-default value [System.SingleUserMode] = [no]
[2017.09.19 15:42:57] [0000m.00s.072ms] [3] S: Config loaded
[2017.09.19 15:42:57] [0000m.00s.102ms] [0] S: Project path [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb] on file system [NTFS]
[2017.09.19 15:42:57] [0000m.00s.102ms] [0] S: Project global path [\\berg\data\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb] on file system [NTFS]
[2017.09.19 15:42:57] [0000m.00s.103ms] [0] S: Project file (.prj) path [\\berg\data\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\FC-PCI-1R0.prj] on file system [UNKNOWN]
[2017.09.19 15:42:57] [0000m.00s.104ms] [0] S: Project file (.prj) local path [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\FC-PCI-1R0.prj] on file system [NTFS]
[2017.09.19 15:42:58] [0000m.00s.108ms] [1] S: WARNING: Database auto-repair support DISABLED
[2017.09.19 15:42:58] [0000m.00s.108ms] [0] S: Multi-user mode (config)
[2017.09.19 15:42:58] [0000m.00s.108ms] [0] S: Event polling mode autodetection
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] S: Started up automatically by iCDB Client: W2130:levk:6884
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] S: Auto close mode
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] S: Database ID [9158-59ed-635f-dd63-6b0f-fa9b-b0ff-a950-beae-8c0c-2cd9-86c5]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: BEGIN dumping
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: Local -> global path prefix list
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [V:\] -> [\\SQLSERVER\Software\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [W:\] -> [\\SQLSERVER\AppDistribution\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [X:\] -> [\\BERG\system\Ufolders\levk\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [Y:\] -> [\\berg\programs\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [Z:\] -> [\\berg\data\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: Global -> local path prefix list
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [\\SQLSERVER\AppDistribution\] -> [W:\]
[2017.09.19 15:42:58] [0000m.00s.117ms] [0] PathTranslator: [\\BERG\system\Ufolders\levk\] -> [X:\]
[2017.09.19 15:42:58] [0000m.00s.118ms] [0] PathTranslator: [\\SQLSERVER\Software\] -> [V:\]
[2017.09.19 15:42:58] [0000m.00s.118ms] [0] PathTranslator: [\\berg\programs\] -> [Y:\]
[2017.09.19 15:42:58] [0000m.00s.118ms] [0] PathTranslator: [\\berg\data\] -> [Z:\]
[2017.09.19 15:42:58] [0000m.00s.118ms] [0] PathTranslator: END dumping
[2017.09.19 15:42:58] [0000m.00s.118ms] [0] S: START
[2017.09.19 15:42:58] [0000m.00s.120ms] [0] S: Server startup lock file created
[2017.09.19 15:42:58] [0000m.00s.122ms] [0] S: Listening for client connections on port [10000]
[2017.09.19 15:42:58] [0000m.00s.124ms] [0] S: Server network ID [W2130:192.168.10.119,W2130,W2130.VG.LOCAL:10000]
[2017.09.19 15:42:58] [0000m.00s.124ms] [0] S: Server GUID [446e-c40e-8e2b-622b-2d01-1c97-d011-c950-77fd-8c0c-2cd9-86c5]
[2017.09.19 15:42:58] [0000m.00s.124ms] [0] S: Project GUID [9158-59ed-635f-dd63-6b0f-fa9b-b0ff-a950-beae-8c0c-2cd9-86c5]
[2017.09.19 15:42:58] [0000m.00s.131ms] [0] S: Wrote data to server address file
[2017.09.19 15:42:58] [0000m.00s.134ms] [0] S: Server startup lock file removed
[2017.09.19 15:42:58] [0000m.00s.135ms] [1] ProjectBackupManager: Setting project file (.prj) path: [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\FC-PCI-1R0.prj]
[2017.09.19 15:42:58] [0000m.00s.243ms] [0] S: Plugins loaded: [PIM] [ENetGen70] 
[2017.09.19 15:42:58] [0000m.00s.244ms] [0] S: Local disc access time: 43 us
[2017.09.19 15:42:58] [0000m.00s.244ms] [0] S: File server access time: 210 us
[2017.09.19 15:42:58] [0000m.00s.255ms] [0] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\icdb.dat] size [73968 (72.2 kB)]
[2017.09.19 15:42:58] [0000m.00s.258ms] [1] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\icdb.dat] opened in read-write mode
[2017.09.19 15:42:58] [0000m.00s.261ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2017.09.19 15:42:58] [0000m.00s.261ms] [0] Database GUARD OK: [73968]
[2017.09.19 15:42:58] [0000m.00s.270ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2017.09.19 15:42:58] [0000m.00s.270ms] [0] Database GUARD OK: [73968]
[2017.09.19 15:42:58] [0000m.00s.270ms] [0] SingleFile: [ab06-e095-5029-1e89] SFI version check [1009] [1009]
[2017.09.19 15:42:58] [0000m.00s.271ms] [0] SingleFile: [ab06-e095-5029-1e89] Database SFI header has been read in [1ms 671us]
[2017.09.19 15:42:58] [0000m.00s.278ms] [0] iCDB Server PI: Server & plugin session [205]
[2017.09.19 15:42:58] [0000m.00s.278ms] [0] iCDB Server PI: Opening database [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb]
[2017.09.19 15:42:58] [0000m.00s.278ms] [0] iCDB Server PI: Database [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb] opened
[2017.09.19 15:42:58] [0000m.00s.313ms] [0] iCDB Database: Checking existence of constraint definitions
[2017.09.19 15:42:58] [0000m.00s.313ms] [0] iCDB Database: Checking constraint definitions version
[2017.09.19 15:42:58] [0000m.00s.401ms] [1] iCDB Database: Constraint definitions version [ce_ee.cns=7.10.24;user.cns=bd5a-97c5-3627-126d-4128-4d69-1284-d650-358d-8c0c-2c99-86c5] up to date
[2017.09.19 15:42:58] [0000m.00s.422ms] [0] iCDB Server PI: Initializing plugins
[2017.09.19 15:42:58] [0000m.00s.426ms] [0] iCDB Server PI: Plugins initialized
[2017.09.19 15:42:58] [0000m.00s.426ms] [0] S: iCDB database loaded
[2017.09.19 15:42:58] [0000m.00s.430ms] [0] S: Starting threads
[2017.09.19 15:42:58] [0000m.00s.431ms] [0] BT: Listening for broadcast messages on port [10000]
[2017.09.19 15:42:58] [0000m.00s.433ms] [1] CMT: There are no clients - waiting [10 seconds]
[2017.09.19 15:42:58] [0000m.00s.437ms] [0] IT: Session [206] for host [W2130] user [levk] with process ID [6884] created
[2017.09.19 15:42:58] [0000m.00s.438ms] [1] SC[206]: Registered sub-client [Expedition PCB_21784390] with ID [1] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:42:58] [0000m.00s.499ms] [1] SC[206]: Registered sub-client [EEVM_EEVM_159572348] with ID [2] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:42:58] [0000m.00s.500ms] [1] SC[206]: UnRegistered sub-client [EEVM_EEVM_159572348] with ID [2] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:42:58] [0000m.00s.534ms] [1] CMT: There are [1] clients now: 206
[2017.09.19 15:43:01] [0000m.03s.340ms] [1] SC[206]: Registered sub-client [ExpeditionCrossProber] with ID [3] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:43:03] [0000m.05s.192ms] [1] SC[206]: Registered sub-client [JobPrefsDBPI_21789718] with ID [4] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:43:03] [0000m.05s.204ms] [1] SC[206]: UnRegistered sub-client [JobPrefsDBPI_21789718] with ID [4] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:43:18] [0000m.21s.044ms] [0] DFAMT: File server access time: 258 us
[2017.09.19 15:50:02] [0007m.04s.890ms] [1] SC[206]: Registered sub-client [JobPrefsDBPI_22209281] with ID [5] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:50:02] [0007m.04s.935ms] [1] SC[206]: Registered sub-client [JobPrefsDBPI_22209343] with ID [6] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:50:03] [0007m.05s.884ms] [1] SC[206]: UnRegistered sub-client [JobPrefsDBPI_22209281] with ID [5] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:50:24] [0007m.27s.041ms] [0] IT: Session [207] for host [W2130] user [levk] with process ID [7672] created
[2017.09.19 15:50:24] [0007m.27s.042ms] [1] SC[207]: Registered sub-client [JobPrefsDBPI_22231390] with ID [1] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:24] [0007m.27s.093ms] [1] CMT: There are [2] clients now: 206, 207
[2017.09.19 15:50:25] [0007m.27s.246ms] [1] SC[207]: Registered sub-client [JobPrefsDBPI_22231640] with ID [2] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:25] [0007m.27s.339ms] [1] SC[207]: Registered sub-client [JobPrefsDBPI_22231734] with ID [3] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:25] [0007m.27s.370ms] [1] SC[207]: Registered sub-client [JobPrefsDBPI_22231765] with ID [4] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:25] [0007m.27s.388ms] [1] SC[207]: UnRegistered sub-client [JobPrefsDBPI_22231734] with ID [3] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:25] [0007m.27s.389ms] [1] SC[207]: UnRegistered sub-client [JobPrefsDBPI_22231765] with ID [4] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:28] [0007m.30s.425ms] [1] SC[207]: UnRegistered sub-client [JobPrefsDBPI_22231640] with ID [2] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:28] [0007m.30s.428ms] [1] SC[207]: UnRegistered sub-client [JobPrefsDBPI_22231390] with ID [1] for session ID [207] host [W2130] user [levk] process ID [7672]
[2017.09.19 15:50:28] [0007m.30s.522ms] [1] CMT: Removed client [207]
[2017.09.19 15:50:28] [0007m.30s.522ms] [1] CMT: There are [1] clients now: 206
[2017.09.19 15:51:27] [0008m.29s.869ms] [0] IT: Session [208] for host [W2130] user [levk] with process ID [7076] created
[2017.09.19 15:51:27] [0008m.29s.870ms] [1] SC[208]: Registered sub-client [JobPrefsDBPI_22294203] with ID [1] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:27] [0008m.29s.890ms] [1] CMT: There are [2] clients now: 206, 208
[2017.09.19 15:51:27] [0008m.30s.070ms] [1] SC[208]: Registered sub-client [JobPrefsDBPI_22294468] with ID [2] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.152ms] [1] SC[208]: Registered sub-client [JobPrefsDBPI_22294546] with ID [3] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.183ms] [1] SC[208]: Registered sub-client [JobPrefsDBPI_22294578] with ID [4] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.200ms] [1] SC[208]: UnRegistered sub-client [JobPrefsDBPI_22294546] with ID [3] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.201ms] [1] SC[208]: UnRegistered sub-client [JobPrefsDBPI_22294578] with ID [4] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.466ms] [1] SC[208]: UnRegistered sub-client [JobPrefsDBPI_22294468] with ID [2] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.469ms] [1] SC[208]: UnRegistered sub-client [JobPrefsDBPI_22294203] with ID [1] for session ID [208] host [W2130] user [levk] process ID [7076]
[2017.09.19 15:51:28] [0008m.30s.494ms] [1] CMT: Removed client [208]
[2017.09.19 15:51:28] [0008m.30s.494ms] [1] CMT: There are [1] clients now: 206
[2017.09.19 15:51:51] [0008m.53s.789ms] [0] IT: Session [209] for host [W2130] user [levk] with process ID [2740] created
[2017.09.19 15:51:51] [0008m.53s.790ms] [1] SC[209]: Registered sub-client [JobPrefsDBPI_22318125] with ID [1] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:51] [0008m.53s.867ms] [1] CMT: There are [2] clients now: 206, 209
[2017.09.19 15:51:51] [0008m.54s.003ms] [1] SC[209]: Registered sub-client [JobPrefsDBPI_22318390] with ID [2] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:51] [0008m.54s.094ms] [1] SC[209]: Registered sub-client [JobPrefsDBPI_22318484] with ID [3] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.125ms] [1] SC[209]: Registered sub-client [JobPrefsDBPI_22318515] with ID [4] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.143ms] [1] SC[209]: UnRegistered sub-client [JobPrefsDBPI_22318484] with ID [3] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.144ms] [1] SC[209]: UnRegistered sub-client [JobPrefsDBPI_22318515] with ID [4] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.435ms] [1] SC[209]: UnRegistered sub-client [JobPrefsDBPI_22318390] with ID [2] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.438ms] [1] SC[209]: UnRegistered sub-client [JobPrefsDBPI_22318125] with ID [1] for session ID [209] host [W2130] user [levk] process ID [2740]
[2017.09.19 15:51:52] [0008m.54s.477ms] [1] CMT: Removed client [209]
[2017.09.19 15:51:52] [0008m.54s.477ms] [1] CMT: There are [1] clients now: 206
[2017.09.19 15:51:55] [0008m.57s.178ms] [1] SC[206]: UnRegistered sub-client [JobPrefsDBPI_22209343] with ID [6] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:55:58] [0013m.01s.000ms] [1] SC[206]: UnRegistered sub-client [ExpeditionCrossProber] with ID [3] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:55:59] [0013m.01s.367ms] [1] SC[206]: UnRegistered sub-client [Expedition PCB_21784390] with ID [1] for session ID [206] host [W2130] user [levk] process ID [6884]
[2017.09.19 15:55:59] [0013m.01s.384ms] [1] CMT: Removed client [206]
[2017.09.19 15:55:59] [0013m.01s.384ms] [1] CMT: There are no clients left - waiting [1 seconds]
[2017.09.19 15:56:01] [0013m.03s.134ms] [0] CMT: Starting server auto-close
[2017.09.19 15:56:01] [0013m.03s.135ms] [0] S: Closing server
[2017.09.19 15:56:01] [0013m.03s.260ms] [0] iCDB Server PI: Closing plugins
[2017.09.19 15:56:01] [0013m.03s.260ms] [0] iCDB Server PI: Plugins closed
[2017.09.19 15:56:01] [0013m.03s.260ms] [0] iCDB Server PI: Unloading database
[2017.09.19 15:56:01] [0013m.03s.261ms] [0] iCDB Server PI: Saving storage
[2017.09.19 15:56:01] [0013m.03s.261ms] [0] iCDB Server PI: Closing database
[2017.09.19 15:56:01] [0013m.03s.266ms] [1] iCDB Server PI: Stats: Database defragmentation: max[2] avg[1] holes[25%] data[97%]
[2017.09.19 15:56:01] [0013m.03s.267ms] [1] iCDB Server PI: Stats: Database file size [91264 (89.1 kB)]
[2017.09.19 15:56:01] [0013m.03s.269ms] [1] iCDB Server PI: WARNING: Database needs defragmentation!
[2017.09.19 15:56:01] [0013m.03s.275ms] [0] iCDB Server PI: Database closed
[2017.09.19 15:56:01] [0013m.03s.275ms] [0] iCDB Server PI: Defragmenting database
[2017.09.19 15:56:01] [0013m.03s.276ms] [0] iCDB Server PI: Creating database [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb] backup to file [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\cdbback\2017-09-19 15.56.01-8180-d.zip]
[2017.09.19 15:56:01] [0013m.03s.519ms] [0] iCDB Server PI: Database backup: DONE
[2017.09.19 15:56:01] [0013m.03s.530ms] [0] SingleFile: [0000-0000-0000-0000] SFI header version check [1009] [1009]
[2017.09.19 15:56:01] [0013m.03s.530ms] [0] Database GUARD OK: [91264]
[2017.09.19 15:56:01] [0013m.03s.530ms] [0] SingleFile: [ab06-e095-5029-1e89] SFI version check [1009] [1009]
[2017.09.19 15:56:01] [0013m.03s.532ms] [0] SingleFile: [ab06-e095-5029-1e89] Database SFI header has been read in [1ms 943us]
[2017.09.19 15:56:01] [0013m.03s.554ms] [1] iCDB Server PI: Stats: Database file sizes: before[91264 (89.1 kB)], after[73968 (72.2 kB)], gain[17296 (16.9 kB)]
[2017.09.19 15:56:01] [0013m.03s.563ms] [0] Single file [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\icdb.dat] closed with size [73968 (72.2 kB)]
[2017.09.19 15:56:01] [0013m.03s.567ms] [0] iCDB Server PI: Database defragmentation completed successfully
[2017.09.19 15:56:01] [0013m.03s.567ms] [1] BackupTransaction: Removing database backup [Z:\Projects\Boards\VB\COMPULAB\CM-188_FC-PCI_Rev1.0\PCB\keyin.icdb\cdbback\2017-09-19 15.56.01-8180-d.zip]
[2017.09.19 15:56:01] [0013m.03s.571ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [43459] ticks
[2017.09.19 15:56:01] [0013m.03s.571ms] [1] iCDB Server PI: Stats: Total iCDB execution time: [14053] microseconds
[2017.09.19 15:56:01] [0013m.03s.571ms] [1] iCDB Server PI: Stats: Total iCDB commands count: [224]
[2017.09.19 15:56:01] [0013m.03s.571ms] [1] iCDB Server PI: Stats: Average iCDB speed:        [15939] commands per second
[2017.09.19 15:56:01] [0013m.03s.678ms] [0] S: STOP
